Dec 02 17:58:14.149 INFO testing sandbox-ipc-0.4.0 against master#8940af3cea4a9a9deabcaf843b2f8cad9a83fc61 for beta-1.31-5
Dec 02 17:58:14.150 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-6/master#8940af3cea4a9a9deabcaf843b2f8cad9a83fc61:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/beta-1.31-5/master#8940af3cea4a9a9deabcaf843b2f8cad9a83fc61:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +8940af3cea4a9a9deabcaf843b2f8cad9a83fc61-alt build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 02 17:58:14.463 INFO [stdout] 16232b54b88356d3ecd320c24cafbf1f5ccab101883153a768fa459280b9fa71
Dec 02 17:58:14.471 INFO running `"docker" "start" "-a" "16232b54b88356d3ecd320c24cafbf1f5ccab101883153a768fa459280b9fa71"`
Dec 02 17:58:15.424 INFO [stderr] usermod: no changes
Dec 02 17:58:15.591 INFO [stderr]    Compiling bincode v0.9.2
Dec 02 17:58:15.591 INFO [stderr]    Compiling uuid v0.5.1
Dec 02 17:58:17.163 INFO [stderr]    Compiling sandbox-ipc v0.4.0 (/source)
Dec 02 17:58:22.368 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 6.91s
Dec 02 17:58:22.380 INFO [stderr] su: No module specific data is present
Dec 02 17:58:23.381 INFO running `"docker" "inspect" "16232b54b88356d3ecd320c24cafbf1f5ccab101883153a768fa459280b9fa71"`
Dec 02 17:58:23.603 INFO running `"docker" "rm" "-f" "16232b54b88356d3ecd320c24cafbf1f5ccab101883153a768fa459280b9fa71"`
Dec 02 17:58:23.847 INFO [stdout] 16232b54b88356d3ecd320c24cafbf1f5ccab101883153a768fa459280b9fa71
Dec 02 17:58:23.849 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-6/master#8940af3cea4a9a9deabcaf843b2f8cad9a83fc61:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/beta-1.31-5/master#8940af3cea4a9a9deabcaf843b2f8cad9a83fc61:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +8940af3cea4a9a9deabcaf843b2f8cad9a83fc61-alt test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 02 17:58:24.299 INFO [stdout] e8a8aa821b900ece2d3245b12c44806f375e6602c7d4d928788fba5ec40bb522
Dec 02 17:58:24.301 INFO running `"docker" "start" "-a" "e8a8aa821b900ece2d3245b12c44806f375e6602c7d4d928788fba5ec40bb522"`
Dec 02 17:58:25.903 INFO [stderr] usermod: no changes
Dec 02 17:58:26.118 INFO [stderr]    Compiling serde_json v1.0.33
Dec 02 17:58:30.630 INFO [stderr]    Compiling sandbox-ipc v0.4.0 (/source)
Dec 02 17:58:40.610 INFO [stderr] warning: use of deprecated item 'tokio_all::runtime::Runtime::reactor': there is now a reactor per worker thread
Dec 02 17:58:40.611 INFO [stderr]    --> src/io.rs:170:81
Dec 02 17:58:40.611 INFO [stderr]     |
Dec 02 17:58:40.611 INFO [stderr] 170 |         let (a, b) = MessageChannel::<SendableFile, SendableFile>::pair(runtime.reactor(), 8192).unwrap();
Dec 02 17:58:40.611 INFO [stderr]     |                                                                                 ^^^^^^^
Dec 02 17:58:40.642 INFO [stderr]     |
Dec 02 17:58:40.643 INFO [stderr]     = note: #[warn(deprecated)] on by default
Dec 02 17:58:40.643 INFO [stderr] 
Dec 02 17:58:40.907 INFO [stderr] warning: use of deprecated item 'tokio_all::runtime::Runtime::reactor': there is now a reactor per worker thread
Dec 02 17:58:40.908 INFO [stderr]    --> src/shm/mod.rs:122:51
Dec 02 17:58:40.908 INFO [stderr]     |
Dec 02 17:58:40.908 INFO [stderr] 122 |         let (a, b) = MessageChannel::pair(runtime.reactor(), 8192).unwrap();
Dec 02 17:58:40.908 INFO [stderr]     |                                                   ^^^^^^^
Dec 02 17:58:40.908 INFO [stderr] 
Dec 02 17:58:41.275 INFO [stderr] warning: use of deprecated item 'tokio::runtime::Runtime::reactor': there is now a reactor per worker thread
Dec 02 17:58:41.275 INFO [stderr]   --> tests/child_channel.rs:22:66
Dec 02 17:58:41.275 INFO [stderr]    |
Dec 02 17:58:41.275 INFO [stderr] 22 |         let channel = channel_serialized.into_channel(tokio_loop.reactor()).unwrap();
Dec 02 17:58:41.275 INFO [stderr]    |                                                                  ^^^^^^^
Dec 02 17:58:41.275 INFO [stderr]    |
Dec 02 17:58:41.275 INFO [stderr]    = note: #[warn(deprecated)] on by default
Dec 02 17:58:41.275 INFO [stderr] 
Dec 02 17:58:41.277 INFO [stderr] warning: use of deprecated item 'tokio::runtime::Runtime::reactor': there is now a reactor per worker thread
Dec 02 17:58:41.278 INFO [stderr]   --> tests/child_channel.rs:29:104
Dec 02 17:58:41.278 INFO [stderr]    |
Dec 02 17:58:41.278 INFO [stderr] 29 |         let (a, mut child) = MessageChannel::establish_with_child(&mut child_command, 8192, tokio_loop.reactor(), |command, child_channel| {
Dec 02 17:58:41.278 INFO [stderr]    |                                                                                                        ^^^^^^^
Dec 02 17:58:41.283 INFO [stderr] 
Dec 02 17:58:41.863 INFO [stderr] warning: use of deprecated item 'tokio::runtime::Runtime::reactor': there is now a reactor per worker thread
Dec 02 17:58:41.863 INFO [stderr]   --> tests/named_channel.rs:22:84
Dec 02 17:58:41.863 INFO [stderr]    |
Dec 02 17:58:41.863 INFO [stderr] 22 |         let channel = NamedMessageChannel::connect(&channel_name, None, tokio_loop.reactor(), 8192).unwrap();
Dec 02 17:58:41.863 INFO [stderr]    |                                                                                    ^^^^^^^
Dec 02 17:58:41.863 INFO [stderr]    |
Dec 02 17:58:41.863 INFO [stderr]    = note: #[warn(deprecated)] on by default
Dec 02 17:58:41.863 INFO [stderr] 
Dec 02 17:58:41.863 INFO [stderr] warning: use of deprecated item 'tokio::runtime::Runtime::reactor': there is now a reactor per worker thread
Dec 02 17:58:41.863 INFO [stderr]   --> tests/named_channel.rs:27:66
Dec 02 17:58:41.863 INFO [stderr]    |
Dec 02 17:58:41.863 INFO [stderr] 27 |         let channel_server = NamedMessageChannel::new(tokio_loop.reactor(), 8192).unwrap();
Dec 02 17:58:41.863 INFO [stderr]    |                                                                  ^^^^^^^
Dec 02 17:58:41.863 INFO [stderr] 
Dec 02 17:58:52.883 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 26.95s
Dec 02 17:58:52.894 INFO [stderr] su: No module specific data is present
Dec 02 17:58:54.094 INFO running `"docker" "inspect" "e8a8aa821b900ece2d3245b12c44806f375e6602c7d4d928788fba5ec40bb522"`
Dec 02 17:58:54.423 INFO running `"docker" "rm" "-f" "e8a8aa821b900ece2d3245b12c44806f375e6602c7d4d928788fba5ec40bb522"`
Dec 02 17:58:54.711 INFO [stdout] e8a8aa821b900ece2d3245b12c44806f375e6602c7d4d928788fba5ec40bb522
Dec 02 17:58:54.713 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-6/master#8940af3cea4a9a9deabcaf843b2f8cad9a83fc61:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/beta-1.31-5/master#8940af3cea4a9a9deabcaf843b2f8cad9a83fc61:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +8940af3cea4a9a9deabcaf843b2f8cad9a83fc61-alt test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 02 17:58:55.325 INFO [stdout] ef718600d9414012129d0fc9a3e39b928e4563e97703bc7c3b953b6f9feae52e
Dec 02 17:58:55.328 INFO running `"docker" "start" "-a" "ef718600d9414012129d0fc9a3e39b928e4563e97703bc7c3b953b6f9feae52e"`
Dec 02 17:58:58.166 INFO [stderr] usermod: no changes
Dec 02 17:58:58.395 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.20s
Dec 02 17:58:58.415 INFO [stderr]      Running /target/debug/deps/sandbox_ipc-1c75f67a712c1238
Dec 02 17:58:58.421 INFO [stdout] 
Dec 02 17:58:58.421 INFO [stdout] running 16 tests
Dec 02 17:58:58.439 INFO [stdout] test channel::tests::pre_raw_message_channel_is_send ... ok
Dec 02 17:58:58.448 INFO [stdout] test shm::tests::big_shm ... ok
Dec 02 17:58:58.448 INFO [stdout] test shm::queue::tests::full_queue_emptied_try_pop ... ok
Dec 02 17:58:58.448 INFO [stdout] test shm::queue::tests::full_queue_try_push ... ok
Dec 02 17:58:58.449 INFO [stdout] test channel::tests::process_handle_is_send ... ok
Dec 02 17:58:58.451 INFO [stdout] test shm::queue::tests::empty_queue_try_pop ... ok
Dec 02 17:58:58.508 INFO [stdout] test shm::tests::shared_mem_is_send ... ok
Dec 02 17:58:58.508 INFO [stdout] test sync::tests::uncontested_mutex_lock ... ok
Dec 02 17:58:58.509 INFO [stdout] test shm::tests::shared_mem_map_is_send ... ok
Dec 02 17:58:58.510 INFO [stdout] test sync::tests::mutex_is_send ... ok
Dec 02 17:58:58.523 INFO [stdout] test tests::raw_message_channel_pair ... ok
Dec 02 17:58:58.535 INFO [stdout] test shm::queue::tests::contested_fill_and_empty ... ok
Dec 02 17:58:58.543 INFO [stdout] test shm::tests::send_mem_same_process ... ok
Dec 02 17:58:58.559 INFO [stdout] test tests::named_message_channel_pair ... ok
Dec 02 17:58:58.587 INFO [stdout] test io::tests::send_file_same_process ... ok
Dec 02 17:58:58.623 INFO [stdout] test sync::tests::single_process_contested_mutex_lock ... ok
Dec 02 17:58:58.623 INFO [stdout] 
Dec 02 17:58:58.623 INFO [stdout] test result: ok. 16 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 02 17:58:58.623 INFO [stdout] 
Dec 02 17:58:58.625 INFO [stderr]      Running /target/debug/deps/child_channel-8a779fcddb19c46b
Dec 02 17:58:58.634 INFO [stdout] parent sent hello
Dec 02 17:58:58.649 INFO [stdout] child received hello
Dec 02 17:58:58.650 INFO [stdout] child sent ehlo
Dec 02 17:58:58.655 INFO [stdout] parent received ehlo
Dec 02 17:58:58.655 INFO [stdout] parent sent file handle
Dec 02 17:58:58.656 INFO [stdout] child received file handle
Dec 02 17:58:58.656 INFO [stdout] child sent file contents
Dec 02 17:58:58.656 INFO [stdout] child sent file handle
Dec 02 17:58:58.657 INFO [stdout] parent received file contents
Dec 02 17:58:58.659 INFO [stdout] parent received file handle
Dec 02 17:58:58.687 INFO [stdout] parent sent file contents
Dec 02 17:58:58.687 INFO [stdout] child received file contents
Dec 02 17:58:58.691 INFO [stdout] parent sent socket
Dec 02 17:58:58.699 INFO [stdout] parent sent mutex
Dec 02 17:58:58.699 INFO [stdout] child received mutex
Dec 02 17:58:58.803 INFO [stdout] child send shared memory write ack
Dec 02 17:58:58.803 INFO [stdout] received shared memory write ack
Dec 02 17:58:58.806 INFO [stderr]      Running /target/debug/deps/named_channel-71f367ba8208eea6
Dec 02 17:58:58.823 INFO [stdout] parent sent hello
Dec 02 17:58:58.839 INFO [stdout] child received hello
Dec 02 17:58:58.843 INFO [stdout] parent received ehlo
Dec 02 17:58:58.843 INFO [stdout] parent sent file handle
Dec 02 17:58:58.844 INFO [stdout] child sent ehlo
Dec 02 17:58:58.851 INFO [stdout] child received file handle
Dec 02 17:58:58.851 INFO [stdout] child sent file contents
Dec 02 17:58:58.851 INFO [stdout] parent received file contents
Dec 02 17:58:58.852 INFO [stdout] parent received file handle
Dec 02 17:58:58.852 INFO [stdout] parent sent file contents
Dec 02 17:58:58.852 INFO [stdout] child sent file handle
Dec 02 17:58:58.860 INFO [stdout] child received file contents
Dec 02 17:58:58.875 INFO [stdout] parent sent socket
Dec 02 17:58:58.875 INFO [stdout] parent sent mutex
Dec 02 17:58:58.876 INFO [stdout] child received mutex
Dec 02 17:58:58.976 INFO [stdout] received shared memory write ack
Dec 02 17:58:58.976 INFO [stdout] child send shared memory write ack
Dec 02 17:58:58.981 INFO [stderr]    Doc-tests sandbox-ipc
Dec 02 17:59:03.271 INFO [stdout] 
Dec 02 17:59:03.271 INFO [stdout] running 1 test
Dec 02 17:59:10.501 INFO [stdout] test src/lib.rs -  (line 7) ... ok
Dec 02 17:59:10.501 INFO [stdout] 
Dec 02 17:59:10.502 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 02 17:59:10.502 INFO [stdout] 
Dec 02 17:59:10.519 INFO [stderr] su: No module specific data is present
Dec 02 17:59:11.172 INFO running `"docker" "inspect" "ef718600d9414012129d0fc9a3e39b928e4563e97703bc7c3b953b6f9feae52e"`
Dec 02 17:59:11.409 INFO running `"docker" "rm" "-f" "ef718600d9414012129d0fc9a3e39b928e4563e97703bc7c3b953b6f9feae52e"`
Dec 02 17:59:11.670 INFO [stdout] ef718600d9414012129d0fc9a3e39b928e4563e97703bc7c3b953b6f9feae52e
